[INFO] cloning repository https://github.com/bjansen/ruboy
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/bjansen/ruboy" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fbjansen%2Fruboy", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fbjansen%2Fruboy'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] b3e5dcb1836d256fb4e526ff42898fa9a9cf0bd7
[INFO] testing bjansen/ruboy against try#28f95933dc0727396c07b48d0a8cb5211b7fb472 for pr-154065-2
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fbjansen%2Fruboy" "/workspace/builds/worker-7-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-7-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/bjansen/ruboy
[INFO] finished tweaking git repo https://github.com/bjansen/ruboy
[INFO] tweaked toml for git repo https://github.com/bjansen/ruboy written to /workspace/builds/worker-7-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/bjansen/ruboy on toolchain 28f95933dc0727396c07b48d0a8cb5211b7fb472
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/bjansen/ruboy already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] d1109ff69a7ab01f0d852f3e5210baf3bed4ffff1a5ce10866b367054d9ea942
[INFO] running `Command { std: "docker" "start" "-a" "d1109ff69a7ab01f0d852f3e5210baf3bed4ffff1a5ce10866b367054d9ea942", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d1109ff69a7ab01f0d852f3e5210baf3bed4ffff1a5ce10866b367054d9ea942", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d1109ff69a7ab01f0d852f3e5210baf3bed4ffff1a5ce10866b367054d9ea942", kill_on_drop: false }`
[INFO] [stdout] d1109ff69a7ab01f0d852f3e5210baf3bed4ffff1a5ce10866b367054d9ea942
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 61113973992a5274108bbb492d12d306bce9063efa3698193dcb1b8bd26835a9
[INFO] running `Command { std: "docker" "start" "-a" "61113973992a5274108bbb492d12d306bce9063efa3698193dcb1b8bd26835a9", kill_on_drop: false }`
[INFO] [stderr]    Compiling ruboy v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.45s
[INFO] running `Command { std: "docker" "inspect" "61113973992a5274108bbb492d12d306bce9063efa3698193dcb1b8bd26835a9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "61113973992a5274108bbb492d12d306bce9063efa3698193dcb1b8bd26835a9", kill_on_drop: false }`
[INFO] [stdout] 61113973992a5274108bbb492d12d306bce9063efa3698193dcb1b8bd26835a9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 9425e6f7086cad471a9259537dea089fdba3381d81b6cbb4c81cca4d3e0c849b
[INFO] running `Command { std: "docker" "start" "-a" "9425e6f7086cad471a9259537dea089fdba3381d81b6cbb4c81cca4d3e0c849b", kill_on_drop: false }`
[INFO] [stderr]    Compiling ruboy v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: function `build_cartridge` is never used
[INFO] [stdout]  --> tests/common/mod.rs:4:8
[INFO] [stdout]   |
[INFO] [stdout] 4 | pub fn build_cartridge(program: Vec<u8>) -> Cartridge {
[INFO] [stdout]   |        ^^^^^^^^^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.24s
[INFO] running `Command { std: "docker" "inspect" "9425e6f7086cad471a9259537dea089fdba3381d81b6cbb4c81cca4d3e0c849b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9425e6f7086cad471a9259537dea089fdba3381d81b6cbb4c81cca4d3e0c849b", kill_on_drop: false }`
[INFO] [stdout] 9425e6f7086cad471a9259537dea089fdba3381d81b6cbb4c81cca4d3e0c849b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 4a02f8b198cd70a1668e7fa4dffa60c8c24b782b3806cdd3955bc9e615de57dc
[INFO] running `Command { std: "docker" "start" "-a" "4a02f8b198cd70a1668e7fa4dffa60c8c24b782b3806cdd3955bc9e615de57dc", kill_on_drop: false }`
[INFO] [stderr] warning: function `assert_flags_eq` is never used
[INFO] [stderr]   --> tests/common/mod.rs:14:8
[INFO] [stderr]    |
[INFO] [stderr] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stderr]    |        ^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `ruboy` (test "test_restart") generated 1 warning
[INFO] [stderr] warning: function `build_cartridge` is never used
[INFO] [stderr]  --> tests/common/mod.rs:4:8
[INFO] [stderr]   |
[INFO] [stderr] 4 | pub fn build_cartridge(program: Vec<u8>) -> Cartridge {
[INFO] [stderr]   |        ^^^^^^^^^^^^^^^
[INFO] [stderr]   |
[INFO] [stderr]   = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `ruboy` (test "test_ret") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `ruboy` (test "test_daa") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `ruboy` (test "test_flags") generated 1 warning
[INFO] [stderr] warning: `ruboy` (test "test_ld") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `ruboy` (test "test_res") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `ruboy` (test "test_8bit_alu") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `ruboy` (test "test_jump") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `ruboy` (test "test_call") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `ruboy` (test "test_stack") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `ruboy` (test "test_set") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `ruboy` (test "test_bit") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `ruboy` (test "test_16bit_arithmetic") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `ruboy` (test "test_misc") generated 1 warning (1 duplicate)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ruboy-ae4feddffc3b5620)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_16bit_arithmetic.rs (/opt/rustwide/target/debug/deps/test_16bit_arithmetic-ba70d12e0b3735b2)
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] test test_ADD_HL_BC ... ok
[INFO] [stdout] test test_ADD_HL_DE ... ok
[INFO] [stdout] test test_ADD_HL_HL ... ok
[INFO] [stdout] test test_ADD_HL_SP ... ok
[INFO] [stdout] test test_DEC_SP ... ok
[INFO] [stdout] test test_DEC_HL ... ok
[INFO] [stdout] test test_DEC_DE ... ok
[INFO] [stdout] test test_ADD_SPn ... ok
[INFO] [stdout] test test_DEC_BC ... ok
[INFO] [stdout] test test_INC_HL ... ok
[INFO] [stdout] test test_INC_SP ... ok
[INFO] [stderr]      Running tests/test_8bit_alu.rs (/opt/rustwide/target/debug/deps/test_8bit_alu-3bb64480b81577b4)
[INFO] [stdout] test test_INC_BC ... ok
[INFO] [stdout] test test_INC_DE ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 89 tests
[INFO] [stdout] test test_ADC_AA ... ok
[INFO] [stdout] test test_ADC_AC ... ok
[INFO] [stdout] test test_ADC_AD ... ok
[INFO] [stdout] test test_ADC_AE ... ok
[INFO] [stdout] test test_ADC_AHL ... ok
[INFO] [stdout] test test_ADC_AL ... ok
[INFO] [stdout] test test_ADC_An ... ok
[INFO] [stdout] test test_ADD_AB ... ok
[INFO] [stdout] test test_ADD_AC ... ok
[INFO] [stdout] test test_ADD_AD ... ok
[INFO] [stdout] test test_ADD_AH ... ok
[INFO] [stdout] test test_ADD_AE ... ok
[INFO] [stdout] test test_ADD_AHL ... ok
[INFO] [stdout] test test_ADD_AL ... ok
[INFO] [stdout] test test_ADD_flags ... ok
[INFO] [stdout] test test_ADD_An ... ok
[INFO] [stdout] test test_AND_AA ... ok
[INFO] [stdout] test test_AND_AB ... ok
[INFO] [stdout] test test_AND_AD ... ok
[INFO] [stdout] test test_AND_AE ... ok
[INFO] [stdout] test test_AND_AH ... ok
[INFO] [stdout] test test_AND_AHL ... ok
[INFO] [stdout] test test_AND_AL ... ok
[INFO] [stdout] test test_AND_AC ... ok
[INFO] [stdout] test test_AND_An ... ok
[INFO] [stdout] test test_CP_A ... ok
[INFO] [stdout] test test_CP_B ... ok
[INFO] [stdout] test test_CP_E ... ok
[INFO] [stdout] test test_CP_H ... ok
[INFO] [stdout] test test_CP_C ... ok
[INFO] [stdout] test test_CP_D ... ok
[INFO] [stdout] test test_CP_HL ... ok
[INFO] [stdout] test test_CP_L ... ok
[INFO] [stdout] test test_CP_n ... ok
[INFO] [stdout] test test_DEC_A ... ok
[INFO] [stdout] test test_DEC_B ... ok
[INFO] [stdout] test test_DEC_D ... ok
[INFO] [stdout] test test_DEC_C ... ok
[INFO] [stdout] test test_DEC_E ... ok
[INFO] [stdout] test test_DEC_H ... ok
[INFO] [stdout] test test_DEC_L ... ok
[INFO] [stdout] test test_INC_B ... ok
[INFO] [stdout] test test_DEC_HL ... ok
[INFO] [stdout] test test_INC_A ... ok
[INFO] [stdout] test test_INC_C ... ok
[INFO] [stdout] test test_INC_D ... ok
[INFO] [stdout] test test_INC_E ... ok
[INFO] [stdout] test test_INC_HL ... ok
[INFO] [stdout] test test_INC_H ... ok
[INFO] [stdout] test test_INC_L ... ok
[INFO] [stdout] test test_OR_AB ... ok
[INFO] [stdout] test test_OR_AA ... ok
[INFO] [stdout] test test_OR_AC ... ok
[INFO] [stdout] test test_OR_AE ... ok
[INFO] [stdout] test test_OR_AD ... ok
[INFO] [stdout] test test_OR_AL ... ok
[INFO] [stdout] test test_OR_An ... ok
[INFO] [stdout] test test_SBC_A ... ok
[INFO] [stdout] test test_OR_AH ... ok
[INFO] [stdout] test test_SBC_AHL ... ok
[INFO] [stdout] test test_SBC_An ... ok
[INFO] [stdout] test test_SBC_B ... ok
[INFO] [stdout] test test_SBC_C ... ok
[INFO] [stdout] test test_SBC_E ... ok
[INFO] [stdout] test test_SBC_L ... ok
[INFO] [stdout] test test_SBC_H ... ok
[INFO] [stdout] test test_SUB_An ... ok
[INFO] [stdout] test test_SUB_AHL ... ok
[INFO] [stdout] test test_SBC_D ... ok
[INFO] [stdout] test test_SUB_B ... ok
[INFO] [stdout] test test_SUB_C ... ok
[INFO] [stdout] test test_SUB_A ... ok
[INFO] [stdout] test test_OR_AHL ... ok
[INFO] [stdout] test test_SUB_D ... ok
[INFO] [stdout] test test_SUB_H ... ok
[INFO] [stdout] test test_SUB_L ... ok
[INFO] [stdout] test test_XOR_AA ... ok
[INFO] [stdout] test test_XOR_AB ... ok
[INFO] [stdout] test test_SUB_E ... ok
[INFO] [stdout] test test_XOR_AE ... ok
[INFO] [stdout] test test_XOR_AD ... ok
[INFO] [stdout] test test_XOR_An ... ok
[INFO] [stdout] test test_XOR_AH ... ok
[INFO] [stdout] test test_XOR_AL ... ok
[INFO] [stdout] test test_XOR_AC ... ok
[INFO] [stderr]      Running tests/test_bit.rs (/opt/rustwide/target/debug/deps/test_bit-918dcfb13b5e4732)
[INFO] [stdout] test test_XOR_AHL ... ok
[INFO] [stdout] test test_ADC_AB ... ok
[INFO] [stdout] test test_ADC_AH ... ok
[INFO] [stdout] test test_ADD_AA ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 89 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 64 tests
[INFO] [stdout] test test_BIT_0B ... ok
[INFO] [stdout] test test_BIT_0A ... ok
[INFO] [stdout] test test_BIT_0C ... ok
[INFO] [stdout] test test_BIT_0E ... ok
[INFO] [stdout] test test_BIT_0H ... ok
[INFO] [stdout] test test_BIT_0HL ... ok
[INFO] [stdout] test test_BIT_0L ... ok
[INFO] [stdout] test test_BIT_1B ... ok
[INFO] [stdout] test test_BIT_1C ... ok
[INFO] [stdout] test test_BIT_1D ... ok
[INFO] [stdout] test test_BIT_1E ... ok
[INFO] [stdout] test test_BIT_1H ... ok
[INFO] [stdout] test test_BIT_0D ... ok
[INFO] [stdout] test test_BIT_1L ... ok
[INFO] [stdout] test test_BIT_1HL ... ok
[INFO] [stdout] test test_BIT_2B ... ok
[INFO] [stdout] test test_BIT_2A ... ok
[INFO] [stdout] test test_BIT_1A ... ok
[INFO] [stdout] test test_BIT_2H ... ok
[INFO] [stdout] test test_BIT_2HL ... ok
[INFO] [stdout] test test_BIT_3A ... ok
[INFO] [stdout] test test_BIT_2L ... ok
[INFO] [stdout] test test_BIT_3C ... ok
[INFO] [stdout] test test_BIT_3E ... ok
[INFO] [stdout] test test_BIT_3H ... ok
[INFO] [stdout] test test_BIT_3HL ... ok
[INFO] [stdout] test test_BIT_3D ... ok
[INFO] [stdout] test test_BIT_2C ... ok
[INFO] [stdout] test test_BIT_2D ... ok
[INFO] [stdout] test test_BIT_2E ... ok
[INFO] [stdout] test test_BIT_3B ... ok
[INFO] [stdout] test test_BIT_3L ... ok
[INFO] [stdout] test test_BIT_4D ... ok
[INFO] [stdout] test test_BIT_4E ... ok
[INFO] [stdout] test test_BIT_4H ... ok
[INFO] [stdout] test test_BIT_4L ... ok
[INFO] [stdout] test test_BIT_5A ... ok
[INFO] [stdout] test test_BIT_5B ... ok
[INFO] [stdout] test test_BIT_5C ... ok
[INFO] [stdout] test test_BIT_5E ... ok
[INFO] [stdout] test test_BIT_5D ... ok
[INFO] [stdout] test test_BIT_5HL ... ok
[INFO] [stdout] test test_BIT_5H ... ok
[INFO] [stdout] test test_BIT_5L ... ok
[INFO] [stdout] test test_BIT_6C ... ok
[INFO] [stdout] test test_BIT_6B ... ok
[INFO] [stdout] test test_BIT_6D ... ok
[INFO] [stdout] test test_BIT_6A ... ok
[INFO] [stdout] test test_BIT_6HL ... ok
[INFO] [stdout] test test_BIT_7A ... ok
[INFO] [stdout] test test_BIT_7B ... ok
[INFO] [stdout] test test_BIT_6H ... ok
[INFO] [stdout] test test_BIT_6L ... ok
[INFO] [stdout] test test_BIT_4C ... ok
[INFO] [stdout] test test_BIT_7E ... ok
[INFO] [stdout] test test_BIT_7H ... ok
[INFO] [stdout] test test_BIT_6E ... ok
[INFO] [stdout] test test_BIT_7HL ... ok
[INFO] [stdout] test test_BIT_7C ... ok
[INFO] [stdout] test test_BIT_4A ... ok
[INFO] [stdout] test test_BIT_4B ... ok
[INFO] [stderr]      Running tests/test_blargg.rs (/opt/rustwide/target/debug/deps/test_blargg-7660486e350eb7be)
[INFO] [stdout] test test_BIT_4HL ... ok
[INFO] [stdout] test test_BIT_7D ... ok
[INFO] [stdout] test test_BIT_7L ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 64 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test test_blargg_cpu_instrs_07 ... ok
[INFO] [stdout] test test_blargg_cpu_instrs_06 ... ok
[INFO] [stdout] test test_blargg_cpu_instrs_08 ... ok
[INFO] [stdout] test test_blargg_cpu_instrs_02 ... FAILED
[INFO] [stdout] test test_blargg_cpu_instrs_03 ... ok
[INFO] [stdout] test test_blargg_cpu_instrs_05 ... ok
[INFO] [stdout] test test_blargg_cpu_instrs_04 ... ok
[INFO] [stdout] test test_blargg_cpu_instrs_01 ... ok
[INFO] [stdout] test test_blargg_cpu_instrs ... FAILED
[INFO] [stdout] test test_blargg_cpu_instrs_09 ... ok
[INFO] [stdout] test test_blargg_cpu_instrs_10 ... ok
[INFO] [stdout] test test_blargg_cpu_instrs_11 ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- test_blargg_cpu_instrs_02 stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'test_blargg_cpu_instrs_02' (190) panicked at tests/test_blargg.rs:153:5:
[INFO] [stdout] assertion `left == right` failed: Expected screen output not to contain the word 'Failed'. Screen output:
[INFO] [stdout] ---
[INFO] [stdout] 02-interrupts                                                                                   EI                                                              Failed #2                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                      
[INFO] [stdout] ---
[INFO] [stdout] 
[INFO] [stdout]   left: false
[INFO] [stdout]  right: true
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5b3d34031808 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5b3d34031808 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::trace_unsynchronized::<std[d054f6f42beb1baa]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5b3d34031808 - std[d054f6f42beb1baa]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5b3d34031808 - <<std[d054f6f42beb1baa]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[5a1c3e9896636f3a]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5b3d3404560a - <core[5a1c3e9896636f3a]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5b3d3404560a - core[5a1c3e9896636f3a]::fmt::write
[INFO] [stdout]    6:     0x5b3d34036022 - std[d054f6f42beb1baa]::io::default_write_fmt::<alloc[154f689e5dd3bae5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:622:11
[INFO] [stdout]    7:     0x5b3d34036022 - <alloc[154f689e5dd3bae5]::vec::Vec<u8> as std[d054f6f42beb1baa]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:1977:13
[INFO] [stdout]    8:     0x5b3d340106d6 - <std[d054f6f42beb1baa]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5b3d340106d6 - std[d054f6f42beb1baa]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5b3d34029ac9 - std[d054f6f42beb1baa]::panicking::default_hook
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5b3d33fafa1c - <alloc[154f689e5dd3bae5]::boxed::Box<dyn for<'a, 'b> core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9
[INFO] [stdout]   12:     0x5b3d33fafa1c - test[fad20673b750c10e]::test_main_inner::<test[fad20673b750c10e]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5b3d34029c82 - <alloc[154f689e5dd3bae5]::boxed::Box<dyn for<'a, 'b> core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9
[INFO] [stdout]   14:     0x5b3d34029c82 - std[d054f6f42beb1baa]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5b3d34010792 - std[d054f6f42beb1baa]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5b3d34007fd9 - std[d054f6f42beb1baa]::sys::backtrace::__rust_end_short_backtrace::<std[d054f6f42beb1baa]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5b3d340114ad - __rustc[7ab284efd7f33ea8]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5b3d34045d5c - core[5a1c3e9896636f3a]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5b3d34045c73 - core[5a1c3e9896636f3a]::panicking::assert_failed_inner
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panicking.rs:434:23
[INFO] [stdout]   20:     0x5b3d33f9d99e - core[5a1c3e9896636f3a]::panicking::assert_failed::<bool, bool>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panicking.rs:394:5
[INFO] [stdout]   21:     0x5b3d33f9eb8f - test_blargg[ab6eebcab24c1af5]::assert_result_ok
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_blargg.rs:153:5
[INFO] [stdout]   22:     0x5b3d33f9ef3c - test_blargg[ab6eebcab24c1af5]::test_blargg_cpu_instrs_02
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_blargg.rs:39:5
[INFO] [stdout]   23:     0x5b3d33f9e177 - test_blargg[ab6eebcab24c1af5]::test_blargg_cpu_instrs_02::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_blargg.rs:31:31
[INFO] [stdout]   24:     0x5b3d33fa2726 - <test_blargg[ab6eebcab24c1af5]::test_blargg_cpu_instrs_02::{closure#0} as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5b3d33fa2afb - <fn() -> core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5b3d33fa2afb - test[fad20673b750c10e]::__rust_begin_short_backtrace::<core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>, fn() -> core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:724:18
[INFO] [stdout]   27:     0x5b3d33fb0375 - test[fad20673b750c10e]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:74
[INFO] [stdout]   28:     0x5b3d33fb0375 - <core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   29:     0x5b3d33fb0375 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}>, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40
[INFO] [stdout]   30:     0x5b3d33fb0375 - std[d054f6f42beb1baa]::panicking::catch_unwind::<core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>, core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x5b3d33fb0375 - std[d054f6f42beb1baa]::panic::catch_unwind::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}>, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x5b3d33fb0375 - test[fad20673b750c10e]::run_test_in_process
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:27
[INFO] [stdout]   33:     0x5b3d33fb0375 - test[fad20673b750c10e]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:668:43
[INFO] [stdout]   34:     0x5b3d33faaed4 - test[fad20673b750c10e]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:698:41
[INFO] [stdout]   35:     0x5b3d33faaed4 - std[d054f6f42beb1baa]::sys::backtrace::__rust_begin_short_backtrace::<test[fad20673b750c10e]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x5b3d33fb33f2 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   37:     0x5b3d33fb33f2 - <core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   38:     0x5b3d33fb33f2 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40
[INFO] [stdout]   39:     0x5b3d33fb33f2 - std[d054f6f42beb1baa]::panicking::catch_unwind::<(), core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x5b3d33fb33f2 - std[d054f6f42beb1baa]::panic::catch_unwind::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x5b3d33fb33f2 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   42:     0x5b3d33fb33f2 - <std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1} as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5b3d34030e8f - <alloc[154f689e5dd3bae5]::boxed::Box<dyn core[5a1c3e9896636f3a]::ops::function::FnOnce<(), Output = ()> + core[5a1c3e9896636f3a]::marker::Send> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2277:9
[INFO] [stdout]   44:     0x5b3d34030e8f - <std[d054f6f42beb1baa]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   45:     0x7f7abe93daa4 - <unknown>
[INFO] [stdout]   46:     0x7f7abe9caa64 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test_blargg_cpu_instrs stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'test_blargg_cpu_instrs' (188) panicked at src/cpu.rs:713:41:
[INFO] [stdout] Memory address not supported: 0xff4d
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5b3d34031808 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5b3d34031808 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::trace_unsynchronized::<std[d054f6f42beb1baa]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5b3d34031808 - std[d054f6f42beb1baa]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5b3d34031808 - <<std[d054f6f42beb1baa]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[5a1c3e9896636f3a]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5b3d3404560a - <core[5a1c3e9896636f3a]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5b3d3404560a - core[5a1c3e9896636f3a]::fmt::write
[INFO] [stdout]    6:     0x5b3d34036022 - std[d054f6f42beb1baa]::io::default_write_fmt::<alloc[154f689e5dd3bae5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:622:11
[INFO] [stdout]    7:     0x5b3d34036022 - <alloc[154f689e5dd3bae5]::vec::Vec<u8> as std[d054f6f42beb1baa]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:1977:13
[INFO] [stdout]    8:     0x5b3d340106d6 - <std[d054f6f42beb1baa]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5b3d340106d6 - std[d054f6f42beb1baa]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5b3d34029ac9 - std[d054f6f42beb1baa]::panicking::default_hook
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5b3d33fafa1c - <alloc[154f689e5dd3bae5]::boxed::Box<dyn for<'a, 'b> core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9
[INFO] [stdout]   12:     0x5b3d33fafa1c - test[fad20673b750c10e]::test_main_inner::<test[fad20673b750c10e]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5b3d34029c82 - <alloc[154f689e5dd3bae5]::boxed::Box<dyn for<'a, 'b> core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9
[INFO] [stdout]   14:     0x5b3d34029c82 - std[d054f6f42beb1baa]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5b3d34010792 - std[d054f6f42beb1baa]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5b3d34007fd9 - std[d054f6f42beb1baa]::sys::backtrace::__rust_end_short_backtrace::<std[d054f6f42beb1baa]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5b3d340114ad - __rustc[7ab284efd7f33ea8]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5b3d34045d5c - core[5a1c3e9896636f3a]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5b3d33feb958 - <ruboy[d2861088a48bcef0]::memory::Mmu as core[5a1c3e9896636f3a]::ops::index::Index<u16>>::index
[INFO] [stdout]                                at /opt/rustwide/workdir/src/memory.rs:91:9
[INFO] [stdout]   20:     0x5b3d33fe58bc - <ruboy[d2861088a48bcef0]::cpu::Cpu>::get_operand
[INFO] [stdout]                                at /opt/rustwide/workdir/src/cpu.rs:713:41
[INFO] [stdout]   21:     0x5b3d33fe5dd3 - <ruboy[d2861088a48bcef0]::cpu::Cpu>::run
[INFO] [stdout]                                at /opt/rustwide/workdir/src/cpu.rs:420:38
[INFO] [stdout]   22:     0x5b3d33f9ec87 - test_blargg[ab6eebcab24c1af5]::test_blargg_cpu_instrs
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_blargg.rs:13:9
[INFO] [stdout]   23:     0x5b3d33f9e117 - test_blargg[ab6eebcab24c1af5]::test_blargg_cpu_instrs::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_blargg.rs:7:28
[INFO] [stdout]   24:     0x5b3d33fa26a6 - <test_blargg[ab6eebcab24c1af5]::test_blargg_cpu_instrs::{closure#0} as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5b3d33fa2afb - <fn() -> core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5b3d33fa2afb - test[fad20673b750c10e]::__rust_begin_short_backtrace::<core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>, fn() -> core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:724:18
[INFO] [stdout]   27:     0x5b3d33fb0375 - test[fad20673b750c10e]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:74
[INFO] [stdout]   28:     0x5b3d33fb0375 - <core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   29:     0x5b3d33fb0375 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}>, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40
[INFO] [stdout]   30:     0x5b3d33fb0375 - std[d054f6f42beb1baa]::panicking::catch_unwind::<core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>, core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x5b3d33fb0375 - std[d054f6f42beb1baa]::panic::catch_unwind::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}>, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x5b3d33fb0375 - test[fad20673b750c10e]::run_test_in_process
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:27
[INFO] [stdout]   33:     0x5b3d33fb0375 - test[fad20673b750c10e]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:668:43
[INFO] [stdout]   34:     0x5b3d33faaed4 - test[fad20673b750c10e]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:698:41
[INFO] [stdout]   35:     0x5b3d33faaed4 - std[d054f6f42beb1baa]::sys::backtrace::__rust_begin_short_backtrace::<test[fad20673b750c10e]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x5b3d33fb33f2 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   37:     0x5b3d33fb33f2 - <core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   38:     0x5b3d33fb33f2 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40
[INFO] [stdout]   39:     0x5b3d33fb33f2 - std[d054f6f42beb1baa]::panicking::catch_unwind::<(), core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x5b3d33fb33f2 - std[d054f6f42beb1baa]::panic::catch_unwind::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x5b3d33fb33f2 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   42:     0x5b3d33fb33f2 - <std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1} as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5b3d34030e8f - <alloc[154f689e5dd3bae5]::boxed::Box<dyn core[5a1c3e9896636f3a]::ops::function::FnOnce<(), Output = ()> + core[5a1c3e9896636f3a]::marker::Send> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2277:9
[INFO] [stdout]   44:     0x5b3d34030e8f - <std[d054f6f42beb1baa]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   45:     0x7f7abe93daa4 - <unknown>
[INFO] [stdout]   46:     0x7f7abe9caa64 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     test_blargg_cpu_instrs
[INFO] [stdout]     test_blargg_cpu_instrs_02
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 10 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.58s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--test test_blargg`
[INFO] running `Command { std: "docker" "inspect" "4a02f8b198cd70a1668e7fa4dffa60c8c24b782b3806cdd3955bc9e615de57dc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4a02f8b198cd70a1668e7fa4dffa60c8c24b782b3806cdd3955bc9e615de57dc", kill_on_drop: false }`
[INFO] [stdout] 4a02f8b198cd70a1668e7fa4dffa60c8c24b782b3806cdd3955bc9e615de57dc
